[2019.01.06 13:16:46] [0000m.00s.031ms] [0] WELCOME
[2019.01.06 13:16:46] [0000m.00s.046ms] [1] iCDB Server ver.2.201, qo/7mCRl2n7WnI8FBNrNMA, build:7697479 created 2017-07-05 14:41:58, sources stamp:qo/7mCRl2n7WnI8FBNrNMA
[2019.01.06 13:16:46] [0000m.00s.046ms] [1] Copyright 2017 Mentor Graphics Corporation.  All Rights Reserved.
[2019.01.06 13:16:46] [0000m.00s.046ms] [1] Base flow version [VX.2.1]
[2019.01.06 13:16:46] [0000m.00s.046ms] [1] Install Id [1466835], Flow Id [X-ENTP VX.2.1], Full Flow Name [Xpedition Enterprise X-ENTP VX.2.1], Exact Access Date [2016/11/01]
[2019.01.06 13:16:46] [0000m.00s.046ms] [1] UPDATE Install Info, Install Id [1659404], UPDATE Name [Xpedition Enterprise X-ENTP VX.2.1 - Update 14]
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] Machine [W4051]  IP [10.7.1.10,127.0.0.1]  User [levk]  PID [13324]
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] Operating system [Microsoft Business Edition, 64-bit (build 9200)]
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] Current working dir [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB]
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] PATH [C:\MentorGraphics\EEVX.2.1\SDD_HOME\xe\win32\lib;C:\MentorGraphics\EEVX.2.1\SDD_HOME\common\win32\bin;C:\MentorGraphics\EEVX.2.1\SDD_HOME\common\win32\lib;C:\MentorGraphics\EEVX.2.1\MGC_HOME.ixn\bin;C:\MentorGraphics\EEVX.2.1\MGC_HOME.ixn\lib;C:\MentorGraphics\EEVX.2.1\SDD_HOME\wg\win32\lib;C:\MentorGraphics\EEVX.2.1\SDD_HOME\common\win32\lib;C:\MentorGraphics\EEVX.2.1\SDD_HOME\common\win32\bin;C:\Program Files (x86)\Common Files\Oracle\Java\javapath;C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;%MGC_HOME%\bin;C:\Program Files (x86)\Intel\iCLS Client\;C:\Program Files\Intel\iCLS Client\;C:\ProgramData\Oracle\Java\javapath;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\WINDOWS\System32\WindowsPowerShell\v1.0\;C:\Program Files (x86)\Common Files\Acronis\SnapAPI\;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files\Intel\Intel(R) Management Engine Components\DAL;C:\Program Files (x86)\Intel\Intel(R) Management Engine Components\IPT;C:\Program Files\Intel\Intel(R) Management Engine Components\IPT;C:\Cadence\SPB_16.6\openaccess\bin\win32\opt;C:\Cadence\SPB_16.6\tools\capture;C:\Cadence\SPB_16.6\tools\pspice;C:\Cadence\SPB_16.6\tools\specctra\bin;C:\Cadence\SPB_16.6\tools\fet\bin;C:\Cadence\SPB_16.6\tools\libutil\bin;C:\Cadence\SPB_16.6\tools\bin;C:\Cadence\SPB_16.6\tools\pcb\bin;C:\WINDOWS\System32\OpenSSH\;C:\Program Files\Microsoft SQL Server\Client SDK\ODBC\110\Tools\Binn\;C:\Program Files (x86)\Microsoft SQL Server\120\Tools\Binn\;C:\Program Files\Microsoft SQL Server\120\Tools\Binn\;C:\Program Files\Microsoft SQL Server\120\DTS\Binn\;C:\Program Files (x86)\Windows Kits\8.1\Windows Performance Toolkit\;C:\Program Files (x86)\Altium Designer S09 Viewer\System;C:\Users\levk\AppData\Local\Microsoft\WindowsApps;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\EEVX.2.1\SDD_HOME\layout3d\win32\lib]
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] SDD_HOME [C:\MentorGraphics\EEVX.2.1\SDD_HOME] on file system [NTFS]
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] SDD_PLATFORM [win32]
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] WDIR [C:\WDIR\EEVX.2.1;C:\MentorGraphics\EEVX.2.1\SDD_HOME\standard;]
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] Local iCDB working dir [C:\WDIR\EEVX.2.1\iCDB] on file system [NTFS]
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] S: Config file name [ServerWG.cfg]
[2019.01.06 13:16:46] [0000m.00s.062ms] [2] S: Loading config files
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] Config file [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb\cdbsvr\ServerWG.cfg] not found
[2019.01.06 13:16:46] [0000m.00s.062ms] [1] Config: Non-default value [System.SingleUserMode] = [no]
[2019.01.06 13:16:46] [0000m.00s.062ms] [3] S: Config loaded
[2019.01.06 13:16:46] [0000m.00s.171ms] [0] S: Project path [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb] on file system [NTFS]
[2019.01.06 13:16:46] [0000m.00s.171ms] [0] S: Project global path [\\berg\data\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb] on file system [NTFS]
[2019.01.06 13:16:46] [0000m.00s.171ms] [0] S: Project file (.prj) path [\\berg\data\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\FC-PCI-2R0.prj] on file system [UNKNOWN]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] S: Project file (.prj) local path [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\FC-PCI-2R0.prj] on file system [NTFS]
[2019.01.06 13:16:46] [0000m.00s.187ms] [1] S: WARNING: Database auto-repair support DISABLED
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] S: Multi-user mode (config)
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] S: Event polling mode autodetection
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] S: Started up automatically by iCDB Client: W4051:levk:7636
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] S: Auto close mode
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] S: Database ID [cb5d-e133-8e7e-b823-c933-e2c1-a33e-2c50-6ccc-59a9-f8f5-e5f5]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: BEGIN dumping
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: Local -> global path prefix list
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [C:\WINDOWS\system32\spool\drivers] -> [\\W4051\print$]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [S:\] -> [\\SQLSERVER\SOFTWARE\]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [X:\] -> [\\berg\system\ufolders\levk\]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [Y:\] -> [\\berg\programs\]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [Z:\] -> [\\berg\data\]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: Global -> local path prefix list
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [\\berg\system\ufolders\levk\] -> [X:\]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [\\SQLSERVER\SOFTWARE\] -> [S:\]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [\\berg\programs\] -> [Y:\]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [\\W4051\print$] -> [C:\WINDOWS\system32\spool\drivers]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: [\\berg\data\] -> [Z:\]
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] PathTranslator: END dumping
[2019.01.06 13:16:46] [0000m.00s.187ms] [0] S: START
[2019.01.06 13:16:47] [0000m.00s.203ms] [0] S: Server startup lock file created
[2019.01.06 13:16:47] [0000m.00s.203ms] [0] S: Listening for client connections on port [10001]
[2019.01.06 13:16:47] [0000m.00s.203ms] [0] S: Server network ID [W4051:10.7.1.10,W4051,W4051.VG.LOCAL:10001]
[2019.01.06 13:16:47] [0000m.00s.203ms] [0] S: Server GUID [985f-f007-80c9-d128-e93e-13c3-a3e1-3c50-e18c-59a9-f8f5-e5f5]
[2019.01.06 13:16:47] [0000m.00s.203ms] [0] S: Project GUID [cb5d-e133-8e7e-b823-c933-e2c1-a33e-2c50-6ccc-59a9-f8f5-e5f5]
[2019.01.06 13:16:47] [0000m.00s.234ms] [0] S: Wrote data to server address file
[2019.01.06 13:16:47] [0000m.00s.249ms] [0] S: Server startup lock file removed
[2019.01.06 13:16:47] [0000m.00s.249ms] [1] ProjectBackupManager: Setting project file (.prj) path: [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\FC-PCI-2R0.prj]
[2019.01.06 13:16:47] [0000m.00s.499ms] [0] S: Plugins loaded: [PIM] [ENetGen70] 
[2019.01.06 13:16:47] [0000m.00s.499ms] [0] S: Local disc access time: 45 us
[2019.01.06 13:16:47] [0000m.00s.499ms] [0] S: File server access time: 2556 us
[2019.01.06 13:16:47] [0000m.00s.499ms] [0] S: Server will not release in-memory storage after read (memory usage overhead) - for better performance
[2019.01.06 13:16:47] [0000m.00s.546ms] [0] Single file [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb\icdb.dat] size [90112 (88.0 kB)]
[2019.01.06 13:16:47] [0000m.00s.562ms] [1] Single file [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb\icdb.dat] opened in read-write mode
[2019.01.06 13:16:47] [0000m.00s.577ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2019.01.06 13:16:47] [0000m.00s.577ms] [0] Database GUARD OK: [90112]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] Database GUARD OK: [90112]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] Database GUARD OK: [90112]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] Database GUARD OK: [90112]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] Database GUARD OK: [90112]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] SingleFile: [e16d-2e9e-1ba2-da79] SFI version check [1009] [1009]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] SingleFile: [e16d-2e9e-1ba2-da79] Database SFI header has been read in [959us]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] iCDB Server PI: Server & plugin session [222]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] iCDB Server PI: Opening database [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb]
[2019.01.06 13:16:47] [0000m.00s.593ms] [0] iCDB Server PI: Database [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb] opened
[2019.01.06 13:16:47] [0000m.00s.624ms] [0] iCDB Database: Checking existence of constraint definitions
[2019.01.06 13:16:47] [0000m.00s.624ms] [0] iCDB Database: Checking constraint definitions version
[2019.01.06 13:16:47] [0000m.00s.671ms] [1] iCDB Database: Constraint definitions version [ce_ee.cns=7.10.56;user.cns=c653-7cf0-7f62-5373-04cb-3ab5-4cb3-ab50-60e9-59a9-f8f5-e5f5] up to date
[2019.01.06 13:16:47] [0000m.00s.702ms] [0] iCDB Server PI: Initializing plugins
[2019.01.06 13:16:47] [0000m.00s.702ms] [0] iCDB Server PI: Plugins initialized
[2019.01.06 13:16:47] [0000m.00s.702ms] [0] S: iCDB database loaded
[2019.01.06 13:16:47] [0000m.00s.702ms] [0] S: Starting threads
[2019.01.06 13:16:47] [0000m.00s.702ms] [0] BT: Listening for broadcast messages on port [10000]
[2019.01.06 13:16:47] [0000m.00s.702ms] [1] CMT: There are no clients - waiting [10 seconds]
[2019.01.06 13:16:47] [0000m.00s.702ms] [0] IT: Session [223] for host [W4051] user [levk] with process ID [7636] created
[2019.01.06 13:16:47] [0000m.00s.718ms] [0] IT: iCDB Server Monitor session [1] for host [W4051] user [levk] with process ID [7148] created
[2019.01.06 13:16:47] [0000m.00s.718ms] [1] DMT: There are [1] iCDB Server Monitor connected now
[2019.01.06 13:16:47] [0000m.00s.718ms] [1] SC[223]: Registered sub-client [Expedition PCB_2085398015] with ID [1] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 13:16:47] [0000m.00s.718ms] [0] MWT: WindowProc: WM_NCCREATE
[2019.01.06 13:16:47] [0000m.00s.827ms] [1] CMT: There are [1] clients now: 223
[2019.01.06 13:16:47] [0000m.00s.859ms] [1] SC[223]: Registered sub-client [EEVM_EEVM_196184660] with ID [2] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 13:16:47] [0000m.00s.859ms] [1] SC[223]: UnRegistered sub-client [EEVM_EEVM_196184660] with ID [2] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 13:16:49] [0000m.03s.008ms] [1] SC[223]: Registered sub-client [JobPrefsDBPI_2085401171] with ID [3] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 13:16:49] [0000m.03s.102ms] [1] SC[223]: UnRegistered sub-client [JobPrefsDBPI_2085401171] with ID [3] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 13:17:19] [0000m.32s.689ms] [0] DFAMT: File server access time: 2242 us
[2019.01.06 13:53:13] [0036m.26s.941ms] [1] SC[223]: Registered sub-client [ExpeditionCrossProber] with ID [4] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 14:00:08] [0043m.21s.713ms] [1] SC[223]: Registered sub-client [JobPrefsDBPI_2087999875] with ID [5] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 14:00:09] [0043m.22s.524ms] [1] SC[223]: Registered sub-client [JobPrefsDBPI_2088000687] with ID [6] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 14:00:10] [0043m.23s.641ms] [1] SC[223]: UnRegistered sub-client [JobPrefsDBPI_2088000687] with ID [6] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 14:01:43] [0044m.57s.038ms] [0] IT: Session [224] for host [W4051] user [levk] with process ID [2736] created
[2019.01.06 14:01:43] [0044m.57s.038ms] [1] SC[224]: Registered sub-client [JobPrefsDBPI_2088095109] with ID [1] for session ID [224] host [W4051] user [levk] process ID [2736]
[2019.01.06 14:01:43] [0044m.57s.116ms] [1] CMT: There are [2] clients now: 223, 224
[2019.01.06 14:01:44] [0044m.57s.803ms] [1] SC[224]: Registered sub-client [JobPrefsDBPI_2088095953] with ID [2] for session ID [224] host [W4051] user [levk] process ID [2736]
[2019.01.06 14:01:44] [0044m.58s.116ms] [1] SC[224]: Registered sub-client [JobPrefsDBPI_2088096281] with ID [3] for session ID [224] host [W4051] user [levk] process ID [2736]
[2019.01.06 14:01:45] [0044m.58s.241ms] [1] SC[224]: Registered sub-client [JobPrefsDBPI_2088096390] with ID [4] for session ID [224] host [W4051] user [levk] process ID [2736]
[2019.01.06 14:01:45] [0044m.58s.272ms] [1] SC[224]: UnRegistered sub-client [JobPrefsDBPI_2088096281] with ID [3] for session ID [224] host [W4051] user [levk] process ID [2736]
[2019.01.06 14:01:45] [0044m.58s.272ms] [1] SC[224]: UnRegistered sub-client [JobPrefsDBPI_2088096390] with ID [4] for session ID [224] host [W4051] user [levk] process ID [2736]
[2019.01.06 14:01:46] [0044m.59s.256ms] [1] SC[224]: UnRegistered sub-client [JobPrefsDBPI_2088095953] with ID [2] for session ID [224] host [W4051] user [levk] process ID [2736]
[2019.01.06 14:01:46] [0044m.59s.256ms] [1] SC[224]: UnRegistered sub-client [JobPrefsDBPI_2088095109] with ID [1] for session ID [224] host [W4051] user [levk] process ID [2736]
[2019.01.06 14:01:46] [0044m.59s.303ms] [1] CMT: Removed client [224]
[2019.01.06 14:01:46] [0044m.59s.303ms] [1] CMT: There are [1] clients now: 223
[2019.01.06 14:03:03] [0046m.16s.474ms] [0] IT: Session [225] for host [W4051] user [levk] with process ID [16740] created
[2019.01.06 14:03:03] [0046m.16s.474ms] [1] SC[225]: Registered sub-client [JobPrefsDBPI_2088174500] with ID [1] for session ID [225] host [W4051] user [levk] process ID [16740]
[2019.01.06 14:03:03] [0046m.16s.593ms] [1] CMT: There are [2] clients now: 223, 225
[2019.01.06 14:03:04] [0046m.17s.252ms] [1] SC[225]: Registered sub-client [JobPrefsDBPI_2088175421] with ID [2] for session ID [225] host [W4051] user [levk] process ID [16740]
[2019.01.06 14:03:04] [0046m.17s.574ms] [1] SC[225]: Registered sub-client [JobPrefsDBPI_2088175734] with ID [3] for session ID [225] host [W4051] user [levk] process ID [16740]
[2019.01.06 14:03:04] [0046m.17s.703ms] [1] SC[225]: Registered sub-client [JobPrefsDBPI_2088175875] with ID [4] for session ID [225] host [W4051] user [levk] process ID [16740]
[2019.01.06 14:03:04] [0046m.17s.744ms] [1] SC[225]: UnRegistered sub-client [JobPrefsDBPI_2088175734] with ID [3] for session ID [225] host [W4051] user [levk] process ID [16740]
[2019.01.06 14:03:04] [0046m.17s.745ms] [1] SC[225]: UnRegistered sub-client [JobPrefsDBPI_2088175875] with ID [4] for session ID [225] host [W4051] user [levk] process ID [16740]
[2019.01.06 14:03:05] [0046m.18s.693ms] [1] SC[225]: UnRegistered sub-client [JobPrefsDBPI_2088175421] with ID [2] for session ID [225] host [W4051] user [levk] process ID [16740]
[2019.01.06 14:03:05] [0046m.18s.693ms] [1] SC[225]: UnRegistered sub-client [JobPrefsDBPI_2088174500] with ID [1] for session ID [225] host [W4051] user [levk] process ID [16740]
[2019.01.06 14:03:05] [0046m.18s.724ms] [1] CMT: Removed client [225]
[2019.01.06 14:03:05] [0046m.18s.724ms] [1] CMT: There are [1] clients now: 223
[2019.01.06 14:03:08] [0046m.21s.663ms] [1] SC[223]: UnRegistered sub-client [JobPrefsDBPI_2087999875] with ID [5] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:30:29] [0253m.42s.630ms] [1] SC[223]: Registered sub-client [JobPrefsDBPI_2100620687] with ID [7] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:30:31] [0253m.44s.921ms] [0] IT: Session [226] for host [W4051] user [levk] with process ID [17192] created
[2019.01.06 17:30:31] [0253m.44s.921ms] [1] SC[226]: Registered sub-client [JobPrefsDBPI_2100622859] with ID [1] for session ID [226] host [W4051] user [levk] process ID [17192]
[2019.01.06 17:30:31] [0253m.44s.968ms] [1] CMT: There are [2] clients now: 223, 226
[2019.01.06 17:30:31] [0253m.45s.108ms] [1] SC[226]: Registered sub-client [JobPrefsDBPI_2100623187] with ID [2] for session ID [226] host [W4051] user [levk] process ID [17192]
[2019.01.06 17:30:31] [0253m.45s.187ms] [1] SC[226]: UnRegistered sub-client [JobPrefsDBPI_2100622859] with ID [1] for session ID [226] host [W4051] user [levk] process ID [17192]
[2019.01.06 17:30:33] [0253m.46s.731ms] [1] SC[226]: UnRegistered sub-client [JobPrefsDBPI_2100623187] with ID [2] for session ID [226] host [W4051] user [levk] process ID [17192]
[2019.01.06 17:30:33] [0253m.46s.756ms] [1] CMT: Removed client [226]
[2019.01.06 17:30:33] [0253m.46s.756ms] [1] CMT: There are [1] clients now: 223
[2019.01.06 17:30:49] [0254m.03s.003ms] [1] SC[223]: UnRegistered sub-client [JobPrefsDBPI_2100620687] with ID [7] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:31:03] [0254m.16s.754ms] [1] SC[223]: Registered sub-client [JobPrefsDBPI_2100654843] with ID [8] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:31:03] [0254m.16s.785ms] [1] SC[223]: UnRegistered sub-client [JobPrefsDBPI_2100654843] with ID [8] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:31:03] [0254m.16s.926ms] [1] SC[223]: Registered sub-client [NetClassDBPI_2100655015] with ID [9] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:31:03] [0254m.16s.988ms] [1] SC[223]: UnRegistered sub-client [NetClassDBPI_2100655015] with ID [9] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:31:03] [0254m.17s.051ms] [1] SC[223]: Registered sub-client [JobPrefsDBPI_2100655140] with ID [10] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:31:03] [0254m.17s.082ms] [1] SC[223]: UnRegistered sub-client [JobPrefsDBPI_2100655140] with ID [10] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:31:09] [0254m.22s.556ms] [1] SC[223]: Registered sub-client [JobPrefsDBPI_2100660656] with ID [11] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:31:09] [0254m.23s.166ms] [1] SC[223]: UnRegistered sub-client [JobPrefsDBPI_2100660656] with ID [11] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:31:10] [0254m.23s.798ms] [0] IT: Session [227] for host [W4051] user [levk] with process ID [9024] created
[2019.01.06 17:31:10] [0254m.23s.798ms] [1] SC[227]: Registered sub-client [JobPrefsDBPI_2100661687] with ID [1] for session ID [227] host [W4051] user [levk] process ID [9024]
[2019.01.06 17:31:10] [0254m.23s.814ms] [1] CMT: There are [2] clients now: 223, 227
[2019.01.06 17:31:10] [0254m.23s.814ms] [0] IT: Session [228] for host [W4051] user [levk] with process ID [12404] created
[2019.01.06 17:31:10] [0254m.23s.814ms] [1] SC[228]: Registered sub-client [JobPrefsDBPI_2100661718] with ID [1] for session ID [228] host [W4051] user [levk] process ID [12404]
[2019.01.06 17:31:10] [0254m.23s.814ms] [0] IT: Session [229] for host [W4051] user [levk] with process ID [12804] created
[2019.01.06 17:31:10] [0254m.23s.814ms] [1] SC[229]: Registered sub-client [JobPrefsDBPI_2100661703] with ID [1] for session ID [229] host [W4051] user [levk] process ID [12804]
[2019.01.06 17:31:10] [0254m.23s.923ms] [1] CMT: There are [4] clients now: 223, 227, 228, 229
[2019.01.06 17:31:10] [0254m.24s.017ms] [1] SC[228]: Registered sub-client [NetClassDBPI_2100662093] with ID [2] for session ID [228] host [W4051] user [levk] process ID [12404]
[2019.01.06 17:31:10] [0254m.24s.157ms] [1] SC[227]: Registered sub-client [JobPrefsDBPI_2100662250] with ID [2] for session ID [227] host [W4051] user [levk] process ID [9024]
[2019.01.06 17:31:10] [0254m.24s.173ms] [1] SC[229]: Registered sub-client [JobPrefsDBPI_2100662250] with ID [2] for session ID [229] host [W4051] user [levk] process ID [12804]
[2019.01.06 17:31:11] [0254m.24s.236ms] [1] SC[228]: Registered sub-client [JobPrefsDBPI_2100662328] with ID [3] for session ID [228] host [W4051] user [levk] process ID [12404]
[2019.01.06 17:31:11] [0254m.24s.360ms] [1] SC[229]: Registered sub-client [NetClassDBPI_2100662437] with ID [3] for session ID [229] host [W4051] user [levk] process ID [12804]
[2019.01.06 17:31:11] [0254m.24s.360ms] [1] SC[227]: Registered sub-client [NetClassDBPI_2100662453] with ID [3] for session ID [227] host [W4051] user [levk] process ID [9024]
[2019.01.06 17:31:11] [0254m.24s.517ms] [1] SC[229]: Registered sub-client [Expedition_2100662609] with ID [4] for session ID [229] host [W4051] user [levk] process ID [12804]
[2019.01.06 17:31:11] [0254m.24s.517ms] [1] SC[229]: UnRegistered sub-client [Expedition_2100662609] with ID [4] for session ID [229] host [W4051] user [levk] process ID [12804]
[2019.01.06 17:31:11] [0254m.24s.673ms] [0] IT: Session [230] for host [W4051] user [levk] with process ID [1636] created
[2019.01.06 17:31:11] [0254m.24s.673ms] [1] SC[230]: Registered sub-client [JobPrefsDBPI_2100662671] with ID [1] for session ID [230] host [W4051] user [levk] process ID [1636]
[2019.01.06 17:31:11] [0254m.24s.704ms] [1] CMT: There are [5] clients now: 223, 227, 228, 229, 230
[2019.01.06 17:31:11] [0254m.24s.813ms] [1] SC[228]: UnRegistered sub-client [JobPrefsDBPI_2100662328] with ID [3] for session ID [228] host [W4051] user [levk] process ID [12404]
[2019.01.06 17:31:11] [0254m.24s.813ms] [1] SC[228]: UnRegistered sub-client [JobPrefsDBPI_2100661718] with ID [1] for session ID [228] host [W4051] user [levk] process ID [12404]
[2019.01.06 17:31:11] [0254m.24s.813ms] [1] SC[228]: UnRegistered sub-client [NetClassDBPI_2100662093] with ID [2] for session ID [228] host [W4051] user [levk] process ID [12404]
[2019.01.06 17:31:11] [0254m.24s.860ms] [1] SC[230]: Registered sub-client [JobPrefsDBPI_2100662968] with ID [2] for session ID [230] host [W4051] user [levk] process ID [1636]
[2019.01.06 17:31:11] [0254m.24s.923ms] [1] CMT: Removed client [228]
[2019.01.06 17:31:11] [0254m.24s.923ms] [1] CMT: There are [4] clients now: 223, 227, 229, 230
[2019.01.06 17:31:11] [0254m.24s.985ms] [1] SC[230]: Registered sub-client [NetClassDBPI_2100663078] with ID [3] for session ID [230] host [W4051] user [levk] process ID [1636]
[2019.01.06 17:31:11] [0254m.25s.173ms] [1] SC[230]: UnRegistered sub-client [JobPrefsDBPI_2100662968] with ID [2] for session ID [230] host [W4051] user [levk] process ID [1636]
[2019.01.06 17:31:11] [0254m.25s.173ms] [1] SC[230]: UnRegistered sub-client [JobPrefsDBPI_2100662671] with ID [1] for session ID [230] host [W4051] user [levk] process ID [1636]
[2019.01.06 17:31:11] [0254m.25s.173ms] [1] SC[230]: UnRegistered sub-client [NetClassDBPI_2100663078] with ID [3] for session ID [230] host [W4051] user [levk] process ID [1636]
[2019.01.06 17:31:12] [0254m.25s.251ms] [1] CMT: Removed client [230]
[2019.01.06 17:31:12] [0254m.25s.251ms] [1] CMT: There are [3] clients now: 223, 227, 229
[2019.01.06 17:31:12] [0254m.25s.438ms] [1] SC[229]: UnRegistered sub-client [JobPrefsDBPI_2100662250] with ID [2] for session ID [229] host [W4051] user [levk] process ID [12804]
[2019.01.06 17:31:12] [0254m.25s.438ms] [1] SC[229]: UnRegistered sub-client [JobPrefsDBPI_2100661703] with ID [1] for session ID [229] host [W4051] user [levk] process ID [12804]
[2019.01.06 17:31:12] [0254m.25s.454ms] [1] SC[229]: UnRegistered sub-client [NetClassDBPI_2100662437] with ID [3] for session ID [229] host [W4051] user [levk] process ID [12804]
[2019.01.06 17:31:12] [0254m.25s.470ms] [1] CMT: Removed client [229]
[2019.01.06 17:31:12] [0254m.25s.470ms] [1] CMT: There are [2] clients now: 223, 227
[2019.01.06 17:31:12] [0254m.25s.595ms] [1] SC[227]: UnRegistered sub-client [JobPrefsDBPI_2100662250] with ID [2] for session ID [227] host [W4051] user [levk] process ID [9024]
[2019.01.06 17:31:12] [0254m.25s.595ms] [1] SC[227]: UnRegistered sub-client [JobPrefsDBPI_2100661687] with ID [1] for session ID [227] host [W4051] user [levk] process ID [9024]
[2019.01.06 17:31:12] [0254m.25s.610ms] [1] SC[227]: UnRegistered sub-client [NetClassDBPI_2100662453] with ID [3] for session ID [227] host [W4051] user [levk] process ID [9024]
[2019.01.06 17:31:12] [0254m.25s.689ms] [1] CMT: Removed client [227]
[2019.01.06 17:31:12] [0254m.25s.689ms] [1] CMT: There are [1] clients now: 223
[2019.01.06 17:34:31] [0257m.44s.766ms] [1] SC[223]: Registered sub-client [JobPrefsDBPI_2100862859] with ID [12] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:34:32] [0257m.45s.737ms] [1] SC[223]: UnRegistered sub-client [JobPrefsDBPI_2100862859] with ID [12] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:34:34] [0257m.48s.141ms] [1] SC[223]: UnRegistered sub-client [ExpeditionCrossProber] with ID [4] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:34:35] [0257m.49s.094ms] [1] SC[223]: UnRegistered sub-client [Expedition PCB_2085398015] with ID [1] for session ID [223] host [W4051] user [levk] process ID [7636]
[2019.01.06 17:34:35] [0257m.49s.172ms] [1] CMT: Removed client [223]
[2019.01.06 17:34:35] [0257m.49s.172ms] [1] CMT: There are no clients left - waiting [1 seconds]
[2019.01.06 17:34:36] [0257m.49s.563ms] [1] SDL: The last connected iCDB Server Monitor [1] is waiting for server close
[2019.01.06 17:34:37] [0257m.50s.265ms] [0] CMT: Starting server auto-close
[2019.01.06 17:34:37] [0257m.50s.375ms] [0] S: Closing server
[2019.01.06 17:34:37] [0257m.50s.531ms] [0] iCDB Server PI: Closing plugins
[2019.01.06 17:34:37] [0257m.50s.531ms] [0] iCDB Server PI: Plugins closed
[2019.01.06 17:34:37] [0257m.50s.531ms] [0] iCDB Server PI: Unloading database
[2019.01.06 17:34:37] [0257m.50s.531ms] [0] iCDB Server PI: Saving storage
[2019.01.06 17:34:37] [0257m.50s.531ms] [0] iCDB Server PI: Closing database
[2019.01.06 17:34:37] [0257m.50s.531ms] [1] iCDB Server PI: Stats: Database defragmentation: max[3] avg[1] holes[45%] data[88%]
[2019.01.06 17:34:37] [0257m.50s.531ms] [1] iCDB Server PI: Stats: Database file size [167320 (163.4 kB)]
[2019.01.06 17:34:37] [0257m.50s.531ms] [1] iCDB Server PI: WARNING: Database needs defragmentation!
[2019.01.06 17:34:37] [0257m.50s.562ms] [0] iCDB Server PI: Database closed
[2019.01.06 17:34:37] [0257m.50s.562ms] [0] iCDB Server PI: Defragmenting database
[2019.01.06 17:34:37] [0257m.50s.562ms] [0] iCDB Server PI: Creating database [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb] backup to file [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb\cdbback\2019-01-06 17.34.37-13324-d.zip]
[2019.01.06 17:34:38] [0257m.52s.142ms] [0] iCDB Server PI: Database backup: DONE
[2019.01.06 17:34:38] [0257m.52s.173ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2019.01.06 17:34:38] [0257m.52s.173ms] [0] Database GUARD OK: [167320]
[2019.01.06 17:34:38] [0257m.52s.173ms] [0] SingleFile: [e16d-2e9e-1ba2-da79] SFI version check [1009] [1009]
[2019.01.06 17:34:38] [0257m.52s.173ms] [0] SingleFile: [e16d-2e9e-1ba2-da79] Database SFI header has been read in [2ms 282us]
[2019.01.06 17:34:39] [0257m.52s.204ms] [1] iCDB Server PI: Stats: Database file sizes: before[167320 (163.4 kB)], after[116336 (113.6 kB)], gain[50984 (49.8 kB)]
[2019.01.06 17:34:39] [0257m.52s.235ms] [0] Single file [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb\icdb.dat] closed with size [116336 (113.6 kB)]
[2019.01.06 17:34:39] [0257m.52s.251ms] [0] iCDB Server PI: Database defragmentation completed successfully
[2019.01.06 17:34:39] [0257m.52s.251ms] [1] BackupTransaction: Removing database backup [Z:\Projects\Boards\VB\COMPULAB\CM-203_FC-PCI_Rev2.0\PCB\keyin.icdb\cdbback\2019-01-06 17.34.37-13324-d.zip]
[2019.01.06 17:34:39] [0257m.52s.267ms] [1] iCDB Server PI: Stats: Total iCDB execution time: [81715] ticks
[2019.01.06 17:34:39] [0257m.52s.267ms] [1] iCDB Server PI: Stats: Total iCDB execution time: [24552] microseconds
[2019.01.06 17:34:39] [0257m.52s.267ms] [1] iCDB Server PI: Stats: Total iCDB commands count: [306]
[2019.01.06 17:34:39] [0257m.52s.267ms] [1] iCDB Server PI: Stats: Average iCDB speed:        [12462] commands per second
[2019.01.06 17:34:39] [0257m.52s.282ms] [1] SD[1]: Removing the last connected iCDB Server Monitor [1]
[2019.01.06 17:34:39] [0257m.52s.517ms] [0] MWT: Destroy the shutdown block reason.
[2019.01.06 17:34:39] [0257m.52s.517ms] [0] MWT: STOP
[2019.01.06 17:34:39] [0257m.52s.517ms] [0] S: STOP
